bng-test/usr/local/etc/raddb# cat users
000c.29eb.eb96          Cleartext-Password := "123"

000c.297c.ea3f          Cleartext-Password := "123"

user1                   Cleartext-Password := "pass1"

===

rad_recv: Access-Request packet from host 192.168.3.74 port 53233, id=91, length=219
        User-Name = "000c.29eb.eb96"
        User-Password = "123"
        Service-Type = Framed-User
        Chargeable-User-Identity = ""
        Acct-Session-Id = "28"
        Calling-Station-Id = "MX104-RE0:ps0.1073741831-0/0/0.0:11"
        ERX-Dhcp-Options = 0x3501013204c0a800650c09667265656273642d343707011c02030f060c
        ERX-Dhcp-Mac-Addr = "000c.29eb.eb96"
        Framed-IP-Address = 192.168.0.101
        NAS-Identifier = "MX104-RE0"
        NAS-Port = 11
        NAS-Port-Id = "ps0.1073741831-0/0/0.0:11"
        NAS-Port-Type = Ethernet
# Executing section authorize from file /usr/local/etc/raddb/sites-enabled/default
+group authorize {
++[preprocess] = ok
++[chap] = noop
++[mschap] = noop
++[digest] = noop
[suffix] No '@' in User-Name = "000c.29eb.eb96", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] = noop
[eap] No EAP-Message, not doing EAP
++[eap] = noop
[files] users: Matched entry 000c.29eb.eb96 at line 1
++[files] = ok
++[expiration] = noop
++[logintime] = noop
++[pap] = updated
+} # group authorize = updated
Found Auth-Type = PAP
# Executing group from file /usr/local/etc/raddb/sites-enabled/default
+group PAP {
[pap] login attempt with password "123"
[pap] Using clear text password "123"
[pap] User authenticated successfully
++[pap] = ok
+} # group PAP = ok
Login OK: [000c.29eb.eb96/123] (from client mx104-RE0 port 11 cli MX104-RE0:ps0.1073741831-0/0/0.0:11)
# Executing section post-auth from file /usr/local/etc/raddb/sites-enabled/default
+group post-auth {
++[exec] = noop
+} # group post-auth = noop
Sending Access-Accept of id 91 to 192.168.3.74 port 53233
Finished request 58.
Going to the next request
Waking up in 4.9 seconds.
rad_recv: Accounting-Request packet from host 192.168.3.74 port 53233, id=92, length=257
        User-Name = "000c.29eb.eb96"
        Acct-Status-Type = Start
        Acct-Session-Id = "28"
        Service-Type = Framed-User
        ERX-Attr-177 = 0x506f72742053706565643a2031303030303030306b
        Acct-Authentic = RADIUS
        Acct-Delay-Time = 0
        Calling-Station-Id = "MX104-RE0:ps0.1073741831-0/0/0.0:11"
        ERX-Dhcp-Options = 0x3501013204c0a800650c09667265656273642d343707011c02030f060c
        ERX-Dhcp-Mac-Addr = "000c.29eb.eb96"
        Event-Timestamp = "Oct 16 2014 09:09:00 UTC"
        Framed-IP-Address = 192.168.0.101
        Framed-IP-Netmask = 255.255.255.0
        NAS-Identifier = "MX104-RE0"
        NAS-Port = 11
        NAS-Port-Id = "ps0.1073741831-0/0/0.0:11"
        NAS-Port-Type = Ethernet
# Executing section preacct from file /usr/local/etc/raddb/sites-enabled/default
+group preacct {
++[preprocess] = ok
[acct_unique] Hashing 'NAS-Port = 11,NAS-Identifier = "MX104-RE0",NAS-IP-Address = 192.168.3.74,Acct-Session-Id = "28",User-Name = "000c.29eb.eb96"'
[acct_unique] Acct-Unique-Session-ID = "377cbcf91adc8a83".
++[acct_unique] = ok
[suffix] No '@' in User-Name = "000c.29eb.eb96", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] = noop
++[files] = noop
+} # group preacct = ok
# Executing section accounting from file /usr/local/etc/raddb/sites-enabled/default
+group accounting {
[detail]        expand: %{Packet-Src-IP-Address} -> 192.168.3.74
[detail]        expand: /var/log/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/detail-%Y%m%d -> /var/log/radacct/192.168.3.74/detail-20141016
[detail] /var/log/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/detail-%Y%m%d expands to /var/log/radacct/192.168.3.74/detail-20141016
[detail]        expand: %t -> Thu Oct 16 13:27:56 2014
++[detail] = ok
++[exec] = noop
[attr_filter.accounting_response]       expand: %{User-Name} -> 000c.29eb.eb96
attr_filter: Matched entry DEFAULT at line 12
++[attr_filter.accounting_response] = updated
+} # group accounting = updated
Sending Accounting-Response of id 92 to 192.168.3.74 port 53233
Finished request 59.
Cleaning up request 59 ID 92 with timestamp +5773
Going to the next request
Waking up in 4.8 seconds.
rad_recv: Accounting-Request packet from host 192.168.3.74 port 53233, id=93, length=395
        User-Name = "000c.29eb.eb96"
        Acct-Status-Type = Interim-Update
        Acct-Session-Id = "28"
        Acct-Input-Octets = 0
        Acct-Output-Octets = 0
        Acct-Session-Time = 0
        Acct-Input-Packets = 0
        Acct-Output-Packets = 0
        Service-Type = Framed-User
        ERX-Attr-177 = 0x506f72742053706565643a2031303030303030306b
        Acct-Authentic = RADIUS
        Acct-Delay-Time = 0
        Calling-Station-Id = "MX104-RE0:ps0.1073741831-0/0/0.0:11"
        ERX-Dhcp-Options = 0x3501013204c0a800650c09667265656273642d343707011c02030f060c
        ERX-Dhcp-Mac-Addr = "000c.29eb.eb96"
        Event-Timestamp = "Oct 16 2014 09:09:00 UTC"
        Framed-IP-Address = 192.168.0.101
        Framed-IP-Netmask = 255.255.255.0
        ERX-Input-Gigapkts = 0
        Acct-Input-Gigawords = 0
        NAS-Identifier = "MX104-RE0"
        NAS-Port = 11
        NAS-Port-Id = "ps0.1073741831-0/0/0.0:11"
        NAS-Port-Type = Ethernet
        ERX-Output-Gigapkts = 0
        Acct-Output-Gigawords = 0
        ERX-IPv6-Acct-Input-Octets = 0
        ERX-IPv6-Acct-Output-Octets = 0
        ERX-IPv6-Acct-Input-Packets = 0
        ERX-IPv6-Acct-Output-Packets = 0
        ERX-IPv6-Acct-Input-Gigawords = 0
        ERX-IPv6-Acct-Output-Gigawords = 0
# Executing section preacct from file /usr/local/etc/raddb/sites-enabled/default
+group preacct {
++[preprocess] = ok
[acct_unique] Hashing 'NAS-Port = 11,NAS-Identifier = "MX104-RE0",NAS-IP-Address = 192.168.3.74,Acct-Session-Id = "28",User-Name = "000c.29eb.eb96"'
[acct_unique] Acct-Unique-Session-ID = "377cbcf91adc8a83".
++[acct_unique] = ok
[suffix] No '@' in User-Name = "000c.29eb.eb96", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] = noop
++[files] = noop
+} # group preacct = ok
# Executing section accounting from file /usr/local/etc/raddb/sites-enabled/default
+group accounting {
[detail]        expand: %{Packet-Src-IP-Address} -> 192.168.3.74
[detail]        expand: /var/log/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/detail-%Y%m%d -> /var/log/radacct/192.168.3.74/detail-20141016
[detail] /var/log/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/detail-%Y%m%d expands to /var/log/radacct/192.168.3.74/detail-20141016
[detail]        expand: %t -> Thu Oct 16 13:27:57 2014
++[detail] = ok
++[exec] = noop
[attr_filter.accounting_response]       expand: %{User-Name} -> 000c.29eb.eb96
attr_filter: Matched entry DEFAULT at line 12
++[attr_filter.accounting_response] = updated
+} # group accounting = updated
Sending Accounting-Response of id 93 to 192.168.3.74 port 53233
Finished request 60.
Cleaning up request 60 ID 93 with timestamp +5774
Going to the next request
Waking up in 4.4 seconds.
Cleaning up request 58 ID 91 with timestamp +5773
Ready to process requests.
rad_recv: Access-Request packet from host 192.168.3.74 port 53233, id=94, length=219
        User-Name = "000c.297c.ea3f"
        User-Password = "123"
        Service-Type = Framed-User
        Chargeable-User-Identity = ""
        Acct-Session-Id = "29"
        Calling-Station-Id = "MX104-RE0:ps0.1073741831-0/0/0.0:11"
        ERX-Dhcp-Options = 0x3501013204c0a800660c09667265656273642d353707011c02030f060c
        ERX-Dhcp-Mac-Addr = "000c.297c.ea3f"
        Framed-IP-Address = 192.168.0.102
        NAS-Identifier = "MX104-RE0"
        NAS-Port = 11
        NAS-Port-Id = "ps0.1073741831-0/0/0.0:11"
        NAS-Port-Type = Ethernet
# Executing section authorize from file /usr/local/etc/raddb/sites-enabled/default
+group authorize {
++[preprocess] = ok
++[chap] = noop
++[mschap] = noop
++[digest] = noop
[suffix] No '@' in User-Name = "000c.297c.ea3f", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] = noop
[eap] No EAP-Message, not doing EAP
++[eap] = noop
[files] users: Matched entry 000c.297c.ea3f at line 3
++[files] = ok
++[expiration] = noop
++[logintime] = noop
++[pap] = updated
+} # group authorize = updated
Found Auth-Type = PAP
# Executing group from file /usr/local/etc/raddb/sites-enabled/default
+group PAP {
[pap] login attempt with password "123"
[pap] Using clear text password "123"
[pap] User authenticated successfully
++[pap] = ok
+} # group PAP = ok
Login OK: [000c.297c.ea3f/123] (from client mx104-RE0 port 11 cli MX104-RE0:ps0.1073741831-0/0/0.0:11)
# Executing section post-auth from file /usr/local/etc/raddb/sites-enabled/default
+group post-auth {
++[exec] = noop
+} # group post-auth = noop
Sending Access-Accept of id 94 to 192.168.3.74 port 53233
Finished request 61.
Going to the next request
Waking up in 4.9 seconds.
rad_recv: Accounting-Request packet from host 192.168.3.74 port 53233, id=95, length=257
        User-Name = "000c.297c.ea3f"
        Acct-Status-Type = Start
        Acct-Session-Id = "29"
        Service-Type = Framed-User
        ERX-Attr-177 = 0x506f72742053706565643a2031303030303030306b
        Acct-Authentic = RADIUS
        Acct-Delay-Time = 0
        Calling-Station-Id = "MX104-RE0:ps0.1073741831-0/0/0.0:11"
        ERX-Dhcp-Options = 0x3501013204c0a800660c09667265656273642d353707011c02030f060c
        ERX-Dhcp-Mac-Addr = "000c.297c.ea3f"
        Event-Timestamp = "Oct 16 2014 09:09:08 UTC"
        Framed-IP-Address = 192.168.0.102
        Framed-IP-Netmask = 255.255.255.0
        NAS-Identifier = "MX104-RE0"
        NAS-Port = 11
        NAS-Port-Id = "ps0.1073741831-0/0/0.0:11"
        NAS-Port-Type = Ethernet
# Executing section preacct from file /usr/local/etc/raddb/sites-enabled/default
+group preacct {
++[preprocess] = ok
[acct_unique] Hashing 'NAS-Port = 11,NAS-Identifier = "MX104-RE0",NAS-IP-Address = 192.168.3.74,Acct-Session-Id = "29",User-Name = "000c.297c.ea3f"'
[acct_unique] Acct-Unique-Session-ID = "eadcd0227dde36b5".
++[acct_unique] = ok
[suffix] No '@' in User-Name = "000c.297c.ea3f", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] = noop
++[files] = noop
+} # group preacct = ok
# Executing section accounting from file /usr/local/etc/raddb/sites-enabled/default
+group accounting {
[detail]        expand: %{Packet-Src-IP-Address} -> 192.168.3.74
[detail]        expand: /var/log/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/detail-%Y%m%d -> /var/log/radacct/192.168.3.74/detail-20141016
[detail] /var/log/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/detail-%Y%m%d expands to /var/log/radacct/192.168.3.74/detail-20141016
[detail]        expand: %t -> Thu Oct 16 13:28:05 2014
++[detail] = ok
++[exec] = noop
[attr_filter.accounting_response]       expand: %{User-Name} -> 000c.297c.ea3f
attr_filter: Matched entry DEFAULT at line 12
++[attr_filter.accounting_response] = updated
+} # group accounting = updated
Sending Accounting-Response of id 95 to 192.168.3.74 port 53233
Finished request 62.
Cleaning up request 62 ID 95 with timestamp +5782
Going to the next request
Waking up in 4.9 seconds.
rad_recv: Accounting-Request packet from host 192.168.3.74 port 53233, id=96, length=395
        User-Name = "000c.297c.ea3f"
        Acct-Status-Type = Interim-Update
        Acct-Session-Id = "29"
        Acct-Input-Octets = 0
        Acct-Output-Octets = 0
        Acct-Session-Time = 1
        Acct-Input-Packets = 0
        Acct-Output-Packets = 0
        Service-Type = Framed-User
        ERX-Attr-177 = 0x506f72742053706565643a2031303030303030306b
        Acct-Authentic = RADIUS
        Acct-Delay-Time = 0
        Calling-Station-Id = "MX104-RE0:ps0.1073741831-0/0/0.0:11"
        ERX-Dhcp-Options = 0x3501013204c0a800660c09667265656273642d353707011c02030f060c
        ERX-Dhcp-Mac-Addr = "000c.297c.ea3f"
        Event-Timestamp = "Oct 16 2014 09:09:09 UTC"
        Framed-IP-Address = 192.168.0.102
        Framed-IP-Netmask = 255.255.255.0
        ERX-Input-Gigapkts = 0
        Acct-Input-Gigawords = 0
        NAS-Identifier = "MX104-RE0"
        NAS-Port = 11
        NAS-Port-Id = "ps0.1073741831-0/0/0.0:11"
        NAS-Port-Type = Ethernet
        ERX-Output-Gigapkts = 0
        Acct-Output-Gigawords = 0
        ERX-IPv6-Acct-Input-Octets = 0
        ERX-IPv6-Acct-Output-Octets = 0
        ERX-IPv6-Acct-Input-Packets = 0
        ERX-IPv6-Acct-Output-Packets = 0
        ERX-IPv6-Acct-Input-Gigawords = 0
        ERX-IPv6-Acct-Output-Gigawords = 0
# Executing section preacct from file /usr/local/etc/raddb/sites-enabled/default
+group preacct {
++[preprocess] = ok
[acct_unique] Hashing 'NAS-Port = 11,NAS-Identifier = "MX104-RE0",NAS-IP-Address = 192.168.3.74,Acct-Session-Id = "29",User-Name = "000c.297c.ea3f"'
[acct_unique] Acct-Unique-Session-ID = "eadcd0227dde36b5".
++[acct_unique] = ok
[suffix] No '@' in User-Name = "000c.297c.ea3f", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] = noop
++[files] = noop
+} # group preacct = ok
# Executing section accounting from file /usr/local/etc/raddb/sites-enabled/default
+group accounting {
[detail]        expand: %{Packet-Src-IP-Address} -> 192.168.3.74
[detail]        expand: /var/log/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/detail-%Y%m%d -> /var/log/radacct/192.168.3.74/detail-20141016
[detail] /var/log/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/detail-%Y%m%d expands to /var/log/radacct/192.168.3.74/detail-20141016
[detail]        expand: %t -> Thu Oct 16 13:28:06 2014
++[detail] = ok
++[exec] = noop
[attr_filter.accounting_response]       expand: %{User-Name} -> 000c.297c.ea3f
attr_filter: Matched entry DEFAULT at line 12
++[attr_filter.accounting_response] = updated
+} # group accounting = updated
Sending Accounting-Response of id 96 to 192.168.3.74 port 53233
Finished request 63.
Cleaning up request 63 ID 96 with timestamp +5783
Going to the next request
Waking up in 4.3 seconds.
Cleaning up request 61 ID 94 with timestamp +5782
Ready to process requests.
